--------------------------------- Captured Out ---------------------------------
---- new test ----
1771059329.263 sable_services uid=1001
1771059329.264 sable_services #x1B[2m2026-02-14T08:55:29.263969Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting network state from PeerConfig { name: ServerName("My.Little.Server"), address: "127.0.0.1:56379", fingerprint: "6c316d120233227cfd1229e579dd613cea7699d4" }
1771059329.264 sable_services #x1B[2m2026-02-14T08:55:29.264226Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1771059329), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Could not connect to 127.0.0.1:56379. Last error: I/O error: Connection refused (os error 111)
1771059329.264 sable_services #x1B[2m2026-02-14T08:55:29.264280Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1771059329), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111)
1771059329.265 sable_ircd     uid=1001
1771059329.269 sable_ircd     #x1B[2m2026-02-14T08:55:29.269140Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434027403087872)), timestamp: 1771059329, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1771059329, name: ServerName("My.Little.Server"), ts: 1771059329, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock()
1771059329.269 sable_ircd     #x1B[2m2026-02-14T08:55:29.269266Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message
1771059329.269 sable_ircd     #x1B[2m2026-02-14T08:55:29.269387Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from reap_preclients_timer
1771059329.270 sable_ircd     #x1B[2m2026-02-14T08:55:29.269893Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun#x1B[0m#x1B[2m:#x1B[0m#x1B[1mapply_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mevent#x1B[0m#x1B[2m=#x1B[0mEvent { id: EventId(Snowflake(810434027403087872)), timestamp: 1771059329, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1771059329, name: ServerName("My.Little.Server"), ts: 1771059329, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_server#x1B[0m#x1B[1m{#x1B[0m#x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mNewServer { server: ServerId(1) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m enabling peer My.Little.Server
1771059329.270 sable_ircd     #x1B[2m2026-02-14T08:55:29.270051Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434027403087872)), timestamp: 1771059329, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] })
1771059329.270 sable_ircd     #x1B[2m2026-02-14T08:55:29.270098Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434027403087872)), timestamp: 1771059329, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }
1771059329.270 sable_ircd     #x1B[2m2026-02-14T08:55:29.270174Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434027403087872)), timestamp: 1771059329, change: EventComplete(EventComplete), users_to_notify: [] })
1771059329.270 sable_ircd     #x1B[2m2026-02-14T08:55:29.270214Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434027403087872)), timestamp: 1771059329, change: EventComplete(EventComplete), users_to_notify: [] }
1771059329.270 sable_ircd     #x1B[2m2026-02-14T08:55:29.270425Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434027407282177)), timestamp: 1771059329, clock: EventClock(1 => 810434027403087872), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1771059329 }) }; event clock=EventClock(1 => 810434027403087872) my clock=EventClock(1 => 810434027403087872)
1771059329.271 sable_ircd     #x1B[2m2026-02-14T08:55:29.270501Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message
1771059329.271 sable_ircd     #x1B[2m2026-02-14T08:55:29.270802Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434027407282177)), timestamp: 1771059329, change: EventComplete(EventComplete), users_to_notify: [] })
1771059329.271 sable_ircd     #x1B[2m2026-02-14T08:55:29.270833Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434027407282177)), timestamp: 1771059329, change: EventComplete(EventComplete), users_to_notify: [] }
1771059329.359 sable_ircd     #x1B[2m2026-02-14T08:55:29.359062Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m got new connection #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0mConnectionData { id: ConnectionId(ListenerId(0), 1), remote_addr: 127.0.0.1, tls_info: None }
1771059329.359 sable_ircd     #x1B[2m2026-02-14T08:55:29.359210Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059329.359 sable_ircd     #x1B[2m2026-02-14T08:55:29.359278Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 1)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection
1771059329.359 sable_ircd     #x1B[2m2026-02-14T08:55:29.359361Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 1)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 1): :My.Little.Server NOTICE * :*** Looking up your hostname
1771059329.360 sable_ircd     #x1B[2m2026-02-14T08:55:29.359551Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059329.360 sable_ircd     #x1B[2m2026-02-14T08:55:29.359611Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 1)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"QUIT :chkport"
1771059329.360 sable_ircd     #x1B[2m2026-02-14T08:55:29.359765Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 1): ERROR :Client quit
1771059329.360 sable_ircd     #x1B[2m2026-02-14T08:55:29.359902Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mCloseConnection(ConnectionId(ListenerId(0), 1))
1771059329.360 sable_ircd     #x1B[2m2026-02-14T08:55:29.359951Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::connection_collection#x1B[0m#x1B[2m:#x1B[0m Removing connection ConnectionId(ListenerId(0), 1)
1771059329.361 sable_ircd     #x1B[2m2026-02-14T08:55:29.360447Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m Connection error #x1B[3mconnection#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 1) #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mClosed
1771059329.361 sable_ircd     #x1B[2m2026-02-14T08:55:29.360545Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059329.361 sable_ircd     #x1B[2m2026-02-14T08:55:29.360804Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from auth_events
1771059329.370 sable_services #x1B[2m2026-02-14T08:55:29.369888Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting network state from PeerConfig { name: ServerName("My.Little.Server"), address: "127.0.0.1:56379", fingerprint: "6c316d120233227cfd1229e579dd613cea7699d4" }
1771059329.370 sable_services #x1B[2m2026-02-14T08:55:29.370158Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1771059329), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:56379 (127.0.0.1:56379)
1771059329.375 sable_ircd     #x1B[2m2026-02-14T08:55:29.374741Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::node#x1B[0m#x1B[2m:#x1B[0m Server got state export request; sending
1771059329.380 chkSvs: connects to server.
1771059329.380 chkSvs -> S: NICK chkSvs
1771059329.380 chkSvs -> S: USER chk chk chk chk
1771059329.381 sable_ircd     #x1B[2m2026-02-14T08:55:29.380692Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m got new connection #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0mConnectionData { id: ConnectionId(ListenerId(0), 2), remote_addr: 127.0.0.1, tls_info: None }
1771059329.381 sable_ircd     #x1B[2m2026-02-14T08:55:29.380841Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059329.381 sable_ircd     #x1B[2m2026-02-14T08:55:29.380893Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection
1771059329.381 sable_ircd     #x1B[2m2026-02-14T08:55:29.380974Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server NOTICE * :*** Looking up your hostname
1771059329.381 sable_ircd     #x1B[2m2026-02-14T08:55:29.381156Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059329.381 sable_ircd     #x1B[2m2026-02-14T08:55:29.381220Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"NICK chkSvs"
1771059329.381 sable_ircd     #x1B[2m2026-02-14T08:55:29.381347Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059329.381 sable_ircd     #x1B[2m2026-02-14T08:55:29.381390Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"USER chk chk chk chk"
1771059329.382 sable_ircd     #x1B[2m2026-02-14T08:55:29.381462Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 357, tv_nsec: 447194677 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("chk")), extra_user_params: OnceLock(("chk", "chk")), nick: OnceLock(<uninit>), realname: OnceLock(Realname("chk")), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1771059329.382 sable_ircd     #x1B[2m2026-02-14T08:55:29.381543Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 357, tv_nsec: 447194677 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("chk")), extra_user_params: OnceLock(("chk", "chk")), nick: OnceLock(Nickname("chkSvs")), realname: OnceLock(Realname("chk")), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1771059329.382 sable_ircd     #x1B[2m2026-02-14T08:55:29.381590Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from async_handlers
1771059329.382 sable_ircd     #x1B[2m2026-02-14T08:55:29.382147Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from auth_events
1771059329.382 sable_ircd     #x1B[2m2026-02-14T08:55:29.382187Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m DNS lookup finished for ConnectionId(ListenerId(0), 2): 127.0.0.1/Some(Hostname("localhost"))
1771059329.382 sable_ircd     #x1B[2m2026-02-14T08:55:29.382220Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server NOTICE * :*** Found your hostname: localhost
1771059329.382 sable_ircd     #x1B[2m2026-02-14T08:55:29.382242Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 357, tv_nsec: 447194677 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("chk")), extra_user_params: OnceLock(("chk", "chk")), nick: OnceLock(Nickname("chkSvs")), realname: OnceLock(Realname("chk")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1771059329.382 sable_ircd     #x1B[2m2026-02-14T08:55:29.382283Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mRegisterClient(ConnectionId(ListenerId(0), 2))
1771059329.383 sable_ircd     #x1B[2m2026-02-14T08:55:29.382495Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: User(UserId(Snowflake(810434027877044224))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434027877044225)), NewUserConnection { user: UserId(Snowflake(810434027877044224)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059329 })) }) }; event clock=EventClock(1 => 810434027407282177) my clock=EventClock(1 => 810434027407282177)
1771059329.383 sable_ircd     #x1B[2m2026-02-14T08:55:29.382593Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message
1771059329.383 sable_ircd     #x1B[2m2026-02-14T08:55:29.382872Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(810434027877044224)), 1) }), users_to_notify: [] })
1771059329.383 sable_ircd     #x1B[2m2026-02-14T08:55:29.382912Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(810434027877044224)), 1) }), users_to_notify: [] }
1771059329.383 sable_ircd     #x1B[2m2026-02-14T08:55:29.382983Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(810434027877044224)), 2), connection: UserConnectionId(Snowflake(810434027877044225)) }), users_to_notify: [] })
1771059329.383 sable_ircd     #x1B[2m2026-02-14T08:55:29.383019Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(810434027877044224)), 2), connection: UserConnectionId(Snowflake(810434027877044225)) }), users_to_notify: [] }
1771059329.383 sable_ircd     #x1B[2m2026-02-14T08:55:29.383082Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 001 chkSvs :Welcome to the test Internet Relay Chat network, chkSvs
1771059329.383 sable_ircd     #x1B[2m2026-02-14T08:55:29.383128Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 002 chkSvs :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1771059329.383 sable_ircd     #x1B[2m2026-02-14T08:55:29.383179Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 003 chkSvs :This server was created 2026-02-14 08:55:29.383162320 UTC
1771059329.383 sable_ircd     #x1B[2m2026-02-14T08:55:29.383221Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 004 chkSvs My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1771059329.383 sable_ircd     #x1B[2m2026-02-14T08:55:29.383286Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 005 chkSvs EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server
1771059329.383 sable_ircd     #x1B[2m2026-02-14T08:55:29.383324Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 422 chkSvs :MOTD File is missing
1771059329.384 sable_ircd     #x1B[2m2026-02-14T08:55:29.383384Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :chkSvs!chk@localhost MODE chkSvs +
1771059329.384 sable_ircd     #x1B[2m2026-02-14T08:55:29.383420Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server NOTICE chkSvs :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1771059329.384 sable_ircd     #x1B[2m2026-02-14T08:55:29.383472Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, change: EventComplete(EventComplete), users_to_notify: [] })
1771059329.384 sable_ircd     #x1B[2m2026-02-14T08:55:29.383501Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, change: EventComplete(EventComplete), users_to_notify: [] }
1771059329.417 sable_services #x1B[2m2026-02-14T08:55:29.416431Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Bootstrap message: Message { source_server: (ServerId(1), 1771059329), content: NetworkState(Network { nick_bindings: {}, historic_nick_users: HistoricNickStore { data: {} }, users: {}, historic_users: HistoricUserStore { users: {} }, user_connections: {}, channels: {}, list_mode_entries: {}, channel_topics: {}, channel_invites: {}, memberships: {}, messages: {}, servers: {ServerId(1): Server { id: ServerId(1), epoch: 1771059329, name: ServerName("My.Little.Server"), last_ping: 1771059329, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }}, network_bans: BanRepository { pre_registration_bans: {}, new_connection_bans: {}, pre_sasl_bans: {}, pre_registration_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: ["", "", "", "", "", ""], uint64: [], regex: [] }, fields: {"user_param_1": (1, String(_)), "nick": (2, String(_)), "realname": (0, String(_)), "user_param_2": (3, String(_)), "tls": (0, Boolean(_)), "ip": (0, Ip(_)), "user": (5, String(_)), "host": (4, String(_))} }, new_connection_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: [], uint64: [], regex: [] }, fields: {"tls": (0, Boolean(_)), "ip": (0, Ip(_))} }, pre_sasl_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: [""], uint64: [], regex: [] }, fields: {"mechanism": (0, String(_)), "ip": (0, Ip(_)), "tls": (0, Boolean(_))} } }, audit_log: {}, accounts: {}, nick_registrations: {}, channel_registrations: {}, channel_accesses: {}, channel_roles: {}, current_services: None, current_history_server_id: None, config: NetworkConfig { opers: [OperConfig { name: "operuser", hash: "$6$z5yA.OfGliDoi/R2$BgSsguS6bxAsPSCygDisgDw5JZuo5.88eU3Hyc7/4OaNpeKIxWGjOggeHzOl0xLiZg1vfwxXjOTFN14wG5vNI." }], debug_mode: true, default_roles: {BuiltinOp: ChannelAccessSet(222192934775), BuiltinVoice: ChannelAccessSet(4296081441), BuiltinAll: ChannelAccessSet(1114112)}, alias_users: [AliasUser { nick: Nickname("ChanServ"), user: Username("ChanServ"), host: Hostname("services."), realname: Realname("Channel services compatibility layer"), command_alias: "CS" }, AliasUser { nick: Nickname("NickServ"), user: Username("NickServ"), host: Hostname("services."), realname: Realname("Account services compatibility layer"), command_alias: "NS" }], object_expiry: 60, pingout_duration: 600 }, clock: EventClock(1 => 810434027407282177), cache_default_channel_roles: OnceLock(<uninit>), alias_users: OnceLock(<uninit>) }) }
1771059329.417 sable_services #x1B[2m2026-02-14T08:55:29.416612Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m enabling peer My.Little.Server
1771059329.417 sable_services #x1B[2m2026-02-14T08:55:29.416732Z#x1B[0m #x1B[33m WARN#x1B[0m #x1B[2msable_services::database::jsonfile#x1B[0m#x1B[2m:#x1B[0m Couldn't open database file, starting from empty
1771059329.417 sable_services #x1B[2m2026-02-14T08:55:29.417223Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434028024246272)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1771059329, name: ServerName("My.Little.Services"), ts: 1771059329, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 810434027407282177) my clock=EventClock(1 => 810434027407282177)
1771059329.418 sable_services #x1B[2m2026-02-14T08:55:29.417624Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434028024246272)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1771059329, name: ServerName("My.Little.Services"), ts: 1771059329, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:56379 (127.0.0.1:56379)
1771059329.420 sable_services #x1B[2m2026-02-14T08:55:29.419517Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434028032634881)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177, 99 => 810434028024246272), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1771059329 }) }; event clock=EventClock(1 => 810434027407282177, 99 => 810434028024246272) my clock=EventClock(1 => 810434027407282177, 99 => 810434028024246272)
1771059329.420 sable_services #x1B[2m2026-02-14T08:55:29.419809Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434028032634881)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177, 99 => 810434028024246272), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1771059329 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:56379 (127.0.0.1:56379)
1771059329.420 sable_services #x1B[2m2026-02-14T08:55:29.419898Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun#x1B[0m#x1B[2m:#x1B[0m#x1B[1mapply_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mevent#x1B[0m#x1B[2m=#x1B[0mEvent { id: EventId(Snowflake(810434028024246272)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1771059329, name: ServerName("My.Little.Services"), ts: 1771059329, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_server#x1B[0m#x1B[1m{#x1B[0m#x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mNewServer { server: ServerId(99) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m enabling peer My.Little.Services
1771059329.423 sable_services #x1B[2m2026-02-14T08:55:29.423338Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434028049412098)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177, 99 => 810434028032634881), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 810434027407282177, 99 => 810434028032634881) my clock=EventClock(1 => 810434027407282177, 99 => 810434028032634881)
1771059329.424 sable_services #x1B[2m2026-02-14T08:55:29.423664Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434028049412098)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177, 99 => 810434028032634881), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:56379 (127.0.0.1:56379)
1771059329.424 sable_ircd     #x1B[2m2026-02-14T08:55:29.424398Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434028032634881)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177, 99 => 810434028024246272), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1771059329 }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(810434028032634881)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177, 99 => 810434028024246272), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1771059329 }) }; event clock=EventClock(1 => 810434027407282177, 99 => 810434028024246272) my clock=EventClock(1 => 810434027877044226)
1771059329.425 sable_ircd     #x1B[2m2026-02-14T08:55:29.424464Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434028032634881)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177, 99 => 810434028024246272), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1771059329 }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(810434028024246272))]
1771059329.425 sable_ircd     #x1B[2m2026-02-14T08:55:29.424496Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434028032634881)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177, 99 => 810434028024246272), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1771059329 }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message
1771059329.460 sable_ircd     #x1B[2m2026-02-14T08:55:29.460325Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434028024246272)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1771059329, name: ServerName("My.Little.Services"), ts: 1771059329, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434028024246272)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1771059329, name: ServerName("My.Little.Services"), ts: 1771059329, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 810434027407282177) my clock=EventClock(1 => 810434027877044226)
1771059329.461 sable_ircd     #x1B[2m2026-02-14T08:55:29.460439Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434028024246272)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1771059329, name: ServerName("My.Little.Services"), ts: 1771059329, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(810434028032634881)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177, 99 => 810434028024246272), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1771059329 }) }
1771059329.461 sable_ircd     #x1B[2m2026-02-14T08:55:29.460554Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434028024246272)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1771059329, name: ServerName("My.Little.Services"), ts: 1771059329, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message
1771059329.461 sable_ircd     #x1B[2m2026-02-14T08:55:29.460885Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun#x1B[0m#x1B[2m:#x1B[0m#x1B[1mapply_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mevent#x1B[0m#x1B[2m=#x1B[0mEvent { id: EventId(Snowflake(810434028024246272)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1771059329, name: ServerName("My.Little.Services"), ts: 1771059329, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_server#x1B[0m#x1B[1m{#x1B[0m#x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mNewServer { server: ServerId(99) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m enabling peer My.Little.Services
1771059329.461 sable_ircd     #x1B[2m2026-02-14T08:55:29.461135Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434028024246272)), timestamp: 1771059329, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] })
1771059329.461 sable_ircd     #x1B[2m2026-02-14T08:55:29.461173Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434028024246272)), timestamp: 1771059329, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] }
1771059329.461 sable_ircd     #x1B[2m2026-02-14T08:55:29.461233Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434028024246272)), timestamp: 1771059329, change: EventComplete(EventComplete), users_to_notify: [] })
1771059329.461 sable_ircd     #x1B[2m2026-02-14T08:55:29.461262Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434028024246272)), timestamp: 1771059329, change: EventComplete(EventComplete), users_to_notify: [] }
1771059329.461 sable_ircd     #x1B[2m2026-02-14T08:55:29.461333Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434028032634881)), timestamp: 1771059329, change: EventComplete(EventComplete), users_to_notify: [] })
1771059329.461 sable_ircd     #x1B[2m2026-02-14T08:55:29.461371Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434028032634881)), timestamp: 1771059329, change: EventComplete(EventComplete), users_to_notify: [] }
1771059329.466 sable_services #x1B[2m2026-02-14T08:55:29.466004Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: GetEvent([EventId(Snowflake(810434028024246272))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(810434028024246272))]
1771059329.466 sable_services #x1B[2m2026-02-14T08:55:29.466059Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: GetEvent([EventId(Snowflake(810434028024246272))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events []
1771059329.468 sable_ircd     #x1B[2m2026-02-14T08:55:29.467995Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434028049412098)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177, 99 => 810434028032634881), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434028049412098)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177, 99 => 810434028032634881), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 810434027407282177, 99 => 810434028032634881) my clock=EventClock(1 => 810434027877044226, 99 => 810434028032634881)
1771059329.468 sable_ircd     #x1B[2m2026-02-14T08:55:29.468382Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434028049412098)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177, 99 => 810434028032634881), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434028049412098)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177, 99 => 810434028032634881), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:54003 (127.0.0.1:54003)
1771059329.472 sable_ircd     #x1B[2m2026-02-14T08:55:29.472096Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434028049412098)), timestamp: 1771059329, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] })
1771059329.472 sable_ircd     #x1B[2m2026-02-14T08:55:29.472134Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434028049412098)), timestamp: 1771059329, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] }
1771059329.472 sable_ircd     #x1B[2m2026-02-14T08:55:29.472256Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434028049412098)), timestamp: 1771059329, change: EventComplete(EventComplete), users_to_notify: [] })
1771059329.472 sable_ircd     #x1B[2m2026-02-14T08:55:29.472297Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434028049412098)), timestamp: 1771059329, change: EventComplete(EventComplete), users_to_notify: [] }
1771059329.481 S -> chkSvs: :My.Little.Server NOTICE * :*** Looking up your hostname
1771059329.481 S -> chkSvs: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1771059329.481 S -> chkSvs: :My.Little.Server 001 chkSvs :Welcome to the test Internet Relay Chat network, chkSvs
1771059329.481 S -> chkSvs: :My.Little.Server 002 chkSvs :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1771059329.481 S -> chkSvs: :My.Little.Server 003 chkSvs :This server was created 2026-02-14 08:55:29.383162320 UTC
1771059329.481 S -> chkSvs: :My.Little.Server 004 chkSvs My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1771059329.481 S -> chkSvs: :My.Little.Server 005 chkSvs EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server
1771059329.481 S -> chkSvs: :My.Little.Server 422 chkSvs :MOTD File is missing
1771059329.481 S -> chkSvs: :chkSvs!chk@localhost MODE chkSvs +
1771059329.481 S -> chkSvs: :My.Little.Server NOTICE chkSvs :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1771059329.481 chkSvs -> S: CAP LS 302
1771059329.482 sable_ircd     #x1B[2m2026-02-14T08:55:29.481439Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059329.482 sable_ircd     #x1B[2m2026-02-14T08:55:29.481505Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"CAP LS 302"
1771059329.482 sable_ircd     #x1B[2m2026-02-14T08:55:29.481671Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server CAP * LS :message-tags server-time echo-message sasl=PLAIN,EXTERNAL batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename
1771059329.507 sable_ircd     #x1B[2m2026-02-14T08:55:29.507080Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: BulkEvents([]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: []
1771059329.531 chkSvs -> S: PING synchronize357.597345429
1771059329.531 S -> chkSvs: :My.Little.Server CAP * LS :message-tags server-time echo-message sasl=PLAIN,EXTERNAL batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename
1771059329.532 sable_ircd     #x1B[2m2026-02-14T08:55:29.531585Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059329.532 sable_ircd     #x1B[2m2026-02-14T08:55:29.531647Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize357.597345429"
1771059329.532 sable_ircd     #x1B[2m2026-02-14T08:55:29.531801Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server PONG My.Little.Server :synchronize357.597345429
1771059329.532 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize357.597345429
1771059329.532 chkSvs -> S: QUIT
1771059329.532 chkSvs -> S: PING synchronize357.598495848
1771059329.533 sable_ircd     #x1B[2m2026-02-14T08:55:29.532543Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059329.533 sable_ircd     #x1B[2m2026-02-14T08:55:29.532583Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"QUIT"
1771059329.533 sable_ircd     #x1B[2m2026-02-14T08:55:29.532637Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059329.533 sable_ircd     #x1B[2m2026-02-14T08:55:29.532670Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize357.598495848"
1771059330.036 sable_ircd     #x1B[2m2026-02-14T08:55:30.035898Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): ERROR :Client quit
1771059330.036 sable_ircd     #x1B[2m2026-02-14T08:55:30.036033Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mCloseConnection(ConnectionId(ListenerId(0), 2))
1771059330.036 sable_ircd     #x1B[2m2026-02-14T08:55:30.036060Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::connection_collection#x1B[0m#x1B[2m:#x1B[0m Removing connection ConnectionId(ListenerId(0), 2)
1771059330.036 sable_ircd     #x1B[2m2026-02-14T08:55:30.036237Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, clock: EventClock(1 => 810434027877044226, 99 => 810434028049412098), target: UserConnection(UserConnectionId(Snowflake(810434027877044225))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 810434027877044226, 99 => 810434028049412098) my clock=EventClock(1 => 810434027877044226, 99 => 810434028049412098)
1771059330.036 S -> chkSvs: ERROR :Client quit
1771059330.036 chkSvs: disconnects from server.
1771059330.037 sable_ircd     #x1B[2m2026-02-14T08:55:30.036613Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, clock: EventClock(1 => 810434027877044226, 99 => 810434028049412098), target: UserConnection(UserConnectionId(Snowflake(810434027877044225))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:54003 (127.0.0.1:54003)
1771059330.037 sable_ircd     #x1B[2m2026-02-14T08:55:30.036611Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m Connection error #x1B[3mconnection#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2) #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mClosed
1771059330.037 sable_ircd     #x1B[2m2026-02-14T08:55:30.036729Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059330.037 1: connects to server.
1771059330.037 1 -> S: NICK jilles
1771059330.037 1 -> S: USER r e g :user
1771059330.037 sable_ircd     #x1B[2m2026-02-14T08:55:30.037276Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m got new connection #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0mConnectionData { id: ConnectionId(ListenerId(0), 3), remote_addr: 127.0.0.1, tls_info: None }
1771059330.037 sable_ircd     #x1B[2m2026-02-14T08:55:30.037418Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059330.038 sable_ircd     #x1B[2m2026-02-14T08:55:30.037469Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection
1771059330.038 sable_ircd     #x1B[2m2026-02-14T08:55:30.037541Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server NOTICE * :*** Looking up your hostname
1771059330.038 sable_ircd     #x1B[2m2026-02-14T08:55:30.037696Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059330.038 sable_ircd     #x1B[2m2026-02-14T08:55:30.037778Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"NICK jilles"
1771059330.038 sable_ircd     #x1B[2m2026-02-14T08:55:30.037891Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059330.038 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname
1771059330.038 sable_ircd     #x1B[2m2026-02-14T08:55:30.037947Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"USER r e g :user"
1771059330.038 sable_ircd     #x1B[2m2026-02-14T08:55:30.038052Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 358, tv_nsec: 103773608 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(<uninit>), realname: OnceLock(Realname("user")), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1771059330.038 sable_ircd     #x1B[2m2026-02-14T08:55:30.038155Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 358, tv_nsec: 103773608 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("jilles")), realname: OnceLock(Realname("user")), hostname: OnceLock(<uninit>), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1771059330.038 sable_ircd     #x1B[2m2026-02-14T08:55:30.038210Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from async_handlers
1771059330.039 sable_ircd     #x1B[2m2026-02-14T08:55:30.038814Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from auth_events
1771059330.039 sable_ircd     #x1B[2m2026-02-14T08:55:30.038854Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m DNS lookup finished for ConnectionId(ListenerId(0), 3): 127.0.0.1/Some(Hostname("localhost"))
1771059330.040 sable_ircd     #x1B[2m2026-02-14T08:55:30.038894Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server NOTICE * :*** Found your hostname: localhost
1771059330.040 sable_ircd     #x1B[2m2026-02-14T08:55:30.038896Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434030628507652)), timestamp: 1771059330, clock: EventClock(1 => 810434030620119043, 99 => 810434028049412098), target: User(UserId(Snowflake(810434027877044224))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 810434030620119043, 99 => 810434028049412098) my clock=EventClock(1 => 810434030620119043, 99 => 810434028049412098)
1771059330.040 sable_ircd     #x1B[2m2026-02-14T08:55:30.038933Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 358, tv_nsec: 103773608 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("jilles")), realname: OnceLock(Realname("user")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1771059330.040 sable_ircd     #x1B[2m2026-02-14T08:55:30.038989Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mRegisterClient(ConnectionId(ListenerId(0), 3))
1771059330.040 sable_ircd     #x1B[2m2026-02-14T08:55:30.039278Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434030628507652)), timestamp: 1771059330, clock: EventClock(1 => 810434030620119043, 99 => 810434028049412098), target: User(UserId(Snowflake(810434027877044224))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:54003 (127.0.0.1:54003)
1771059330.040 sable_ircd     #x1B[2m2026-02-14T08:55:30.039282Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(810434027877044224)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(810434027877044225)), user: UserId(Snowflake(810434027877044224)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059329 } }), users_to_notify: [] })
1771059330.040 sable_ircd     #x1B[2m2026-02-14T08:55:30.039330Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(810434027877044224)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(810434027877044225)), user: UserId(Snowflake(810434027877044224)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059329 } }), users_to_notify: [] }
1771059330.040 sable_ircd     #x1B[2m2026-02-14T08:55:30.039393Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, change: EventComplete(EventComplete), users_to_notify: [] })
1771059330.040 sable_ircd     #x1B[2m2026-02-14T08:55:30.039427Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, change: EventComplete(EventComplete), users_to_notify: [] }
1771059330.040 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost
1771059330.043 sable_ircd     #x1B[2m2026-02-14T08:55:30.042724Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434030645284869)), timestamp: 1771059330, clock: EventClock(1 => 810434030628507652, 99 => 810434028049412098), target: User(UserId(Snowflake(810434030632701954))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434030632701955)), NewUserConnection { user: UserId(Snowflake(810434030632701954)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059330 })) }) }; event clock=EventClock(1 => 810434030628507652, 99 => 810434028049412098) my clock=EventClock(1 => 810434030628507652, 99 => 810434028049412098)
1771059330.043 sable_ircd     #x1B[2m2026-02-14T08:55:30.043030Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434030645284869)), timestamp: 1771059330, clock: EventClock(1 => 810434030628507652, 99 => 810434028049412098), target: User(UserId(Snowflake(810434030632701954))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434030632701955)), NewUserConnection { user: UserId(Snowflake(810434030632701954)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059330 })) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:54003 (127.0.0.1:54003)
1771059330.043 sable_ircd     #x1B[2m2026-02-14T08:55:30.043184Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434030628507652)), timestamp: 1771059330, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(810434027877044224)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] })
1771059330.043 sable_ircd     #x1B[2m2026-02-14T08:55:30.043220Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434030628507652)), timestamp: 1771059330, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(810434027877044224)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] }
1771059330.043 sable_ircd     #x1B[2m2026-02-14T08:55:30.043269Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434030628507652)), timestamp: 1771059330, change: EventComplete(EventComplete), users_to_notify: [] })
1771059330.043 sable_ircd     #x1B[2m2026-02-14T08:55:30.043297Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434030628507652)), timestamp: 1771059330, change: EventComplete(EventComplete), users_to_notify: [] }
1771059330.044 sable_services #x1B[2m2026-02-14T08:55:30.043858Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434030628507652)), timestamp: 1771059330, clock: EventClock(1 => 810434030620119043, 99 => 810434028049412098), target: User(UserId(Snowflake(810434027877044224))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(810434030628507652)), timestamp: 1771059330, clock: EventClock(1 => 810434030620119043, 99 => 810434028049412098), target: User(UserId(Snowflake(810434027877044224))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 810434030620119043, 99 => 810434028049412098) my clock=EventClock(1 => 810434027407282177, 99 => 810434028049412098)
1771059330.044 sable_services #x1B[2m2026-02-14T08:55:30.043947Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434030628507652)), timestamp: 1771059330, clock: EventClock(1 => 810434030620119043, 99 => 810434028049412098), target: User(UserId(Snowflake(810434027877044224))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(810434030620119043))]
1771059330.044 sable_services #x1B[2m2026-02-14T08:55:30.044312Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434030628507652)), timestamp: 1771059330, clock: EventClock(1 => 810434030620119043, 99 => 810434028049412098), target: User(UserId(Snowflake(810434027877044224))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434030628507652)), timestamp: 1771059330, clock: EventClock(1 => 810434030620119043, 99 => 810434028049412098), target: User(UserId(Snowflake(810434027877044224))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:56379 (127.0.0.1:56379)
1771059330.046 sable_ircd     #x1B[2m2026-02-14T08:55:30.045443Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434030645284869)), timestamp: 1771059330, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(810434030632701954)), 1) }), users_to_notify: [] })
1771059330.046 sable_ircd     #x1B[2m2026-02-14T08:55:30.045484Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434030645284869)), timestamp: 1771059330, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(810434030632701954)), 1) }), users_to_notify: [] }
1771059330.046 sable_ircd     #x1B[2m2026-02-14T08:55:30.045544Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434030645284869)), timestamp: 1771059330, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(810434030632701954)), 2), connection: UserConnectionId(Snowflake(810434030632701955)) }), users_to_notify: [] })
1771059330.046 sable_ircd     #x1B[2m2026-02-14T08:55:30.045579Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434030645284869)), timestamp: 1771059330, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(810434030632701954)), 2), connection: UserConnectionId(Snowflake(810434030632701955)) }), users_to_notify: [] }
1771059330.046 sable_ircd     #x1B[2m2026-02-14T08:55:30.045642Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 001 jilles :Welcome to the test Internet Relay Chat network, jilles
1771059330.046 sable_ircd     #x1B[2m2026-02-14T08:55:30.045682Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 002 jilles :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1771059330.046 sable_ircd     #x1B[2m2026-02-14T08:55:30.045723Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 003 jilles :This server was created 2026-02-14 08:55:30.045708568 UTC
1771059330.046 sable_ircd     #x1B[2m2026-02-14T08:55:30.045786Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 004 jilles My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1771059330.046 sable_ircd     #x1B[2m2026-02-14T08:55:30.045843Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 005 jilles EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server
1771059330.046 sable_ircd     #x1B[2m2026-02-14T08:55:30.045867Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 422 jilles :MOTD File is missing
1771059330.046 sable_ircd     #x1B[2m2026-02-14T08:55:30.045886Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :jilles!r@localhost MODE jilles +
1771059330.046 sable_ircd     #x1B[2m2026-02-14T08:55:30.045903Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server NOTICE jilles :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1771059330.046 sable_ircd     #x1B[2m2026-02-14T08:55:30.045930Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434030645284869)), timestamp: 1771059330, change: EventComplete(EventComplete), users_to_notify: [] })
1771059330.046 sable_ircd     #x1B[2m2026-02-14T08:55:30.045948Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434030645284869)), timestamp: 1771059330, change: EventComplete(EventComplete), users_to_notify: [] }
1771059330.046 S -> 1: :My.Little.Server 001 jilles :Welcome to the test Internet Relay Chat network, jilles
1771059330.046 S -> 1: :My.Little.Server 002 jilles :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432
1771059330.080 sable_services #x1B[2m2026-02-14T08:55:30.080185Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, clock: EventClock(1 => 810434027877044226, 99 => 810434028049412098), target: UserConnection(UserConnectionId(Snowflake(810434027877044225))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, clock: EventClock(1 => 810434027877044226, 99 => 810434028049412098), target: UserConnection(UserConnectionId(Snowflake(810434027877044225))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 810434027877044226, 99 => 810434028049412098) my clock=EventClock(1 => 810434027407282177, 99 => 810434028049412098)
1771059330.080 sable_services #x1B[2m2026-02-14T08:55:30.080253Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, clock: EventClock(1 => 810434027877044226, 99 => 810434028049412098), target: UserConnection(UserConnectionId(Snowflake(810434027877044225))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(810434027877044226))]
1771059330.081 sable_services #x1B[2m2026-02-14T08:55:30.080669Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, clock: EventClock(1 => 810434027877044226, 99 => 810434028049412098), target: UserConnection(UserConnectionId(Snowflake(810434027877044225))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, clock: EventClock(1 => 810434027877044226, 99 => 810434028049412098), target: UserConnection(UserConnectionId(Snowflake(810434027877044225))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:56379 (127.0.0.1:56379)
1771059330.085 sable_ircd     #x1B[2m2026-02-14T08:55:30.084965Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: GetEvent([EventId(Snowflake(810434030620119043))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(810434030620119043))]
1771059330.085 sable_ircd     #x1B[2m2026-02-14T08:55:30.085019Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: GetEvent([EventId(Snowflake(810434030620119043))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [Event { id: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, clock: EventClock(1 => 810434027877044226, 99 => 810434028049412098), target: UserConnection(UserConnectionId(Snowflake(810434027877044225))), details: UserDisconnect(UserDisconnect) }]
1771059330.086 sable_services #x1B[2m2026-02-14T08:55:30.086011Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434030645284869)), timestamp: 1771059330, clock: EventClock(1 => 810434030628507652, 99 => 810434028049412098), target: User(UserId(Snowflake(810434030632701954))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434030632701955)), NewUserConnection { user: UserId(Snowflake(810434030632701954)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059330 })) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(810434030645284869)), timestamp: 1771059330, clock: EventClock(1 => 810434030628507652, 99 => 810434028049412098), target: User(UserId(Snowflake(810434030632701954))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434030632701955)), NewUserConnection { user: UserId(Snowflake(810434030632701954)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059330 })) }) }; event clock=EventClock(1 => 810434030628507652, 99 => 810434028049412098) my clock=EventClock(1 => 810434027407282177, 99 => 810434028049412098)
1771059330.086 sable_services #x1B[2m2026-02-14T08:55:30.086067Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434030645284869)), timestamp: 1771059330, clock: EventClock(1 => 810434030628507652, 99 => 810434028049412098), target: User(UserId(Snowflake(810434030632701954))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434030632701955)), NewUserConnection { user: UserId(Snowflake(810434030632701954)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059330 })) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(810434030628507652))]
1771059330.086 sable_services #x1B[2m2026-02-14T08:55:30.086342Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434030645284869)), timestamp: 1771059330, clock: EventClock(1 => 810434030628507652, 99 => 810434028049412098), target: User(UserId(Snowflake(810434030632701954))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434030632701955)), NewUserConnection { user: UserId(Snowflake(810434030632701954)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059330 })) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434030645284869)), timestamp: 1771059330, clock: EventClock(1 => 810434030628507652, 99 => 810434028049412098), target: User(UserId(Snowflake(810434030632701954))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434030632701955)), NewUserConnection { user: UserId(Snowflake(810434030632701954)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059330 })) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:56379 (127.0.0.1:56379)
1771059330.121 sable_ircd     #x1B[2m2026-02-14T08:55:30.121004Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: GetEvent([EventId(Snowflake(810434027877044226))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(810434027877044226))]
1771059330.121 sable_ircd     #x1B[2m2026-02-14T08:55:30.121053Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: GetEvent([EventId(Snowflake(810434027877044226))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [Event { id: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: User(UserId(Snowflake(810434027877044224))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434027877044225)), NewUserConnection { user: UserId(Snowflake(810434027877044224)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059329 })) }) }]
1771059330.126 sable_services #x1B[2m2026-02-14T08:55:30.126045Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: BulkEvents([Event { id: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, clock: EventClock(1 => 810434027877044226, 99 => 810434028049412098), target: UserConnection(UserConnectionId(Snowflake(810434027877044225))), details: UserDisconnect(UserDisconnect) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, clock: EventClock(1 => 810434027877044226, 99 => 810434028049412098), target: UserConnection(UserConnectionId(Snowflake(810434027877044225))), details: UserDisconnect(UserDisconnect) }]
1771059330.126 sable_services #x1B[2m2026-02-14T08:55:30.126119Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: BulkEvents([Event { id: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, clock: EventClock(1 => 810434027877044226, 99 => 810434028049412098), target: UserConnection(UserConnectionId(Snowflake(810434027877044225))), details: UserDisconnect(UserDisconnect) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, clock: EventClock(1 => 810434027877044226, 99 => 810434028049412098), target: UserConnection(UserConnectionId(Snowflake(810434027877044225))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 810434027877044226, 99 => 810434028049412098) my clock=EventClock(1 => 810434027407282177, 99 => 810434028049412098)
1771059330.126 sable_services #x1B[2m2026-02-14T08:55:30.126166Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: BulkEvents([Event { id: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, clock: EventClock(1 => 810434027877044226, 99 => 810434028049412098), target: UserConnection(UserConnectionId(Snowflake(810434027877044225))), details: UserDisconnect(UserDisconnect) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(810434027877044226))]
1771059330.128 sable_ircd     #x1B[2m2026-02-14T08:55:30.127923Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: GetEvent([EventId(Snowflake(810434030628507652))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(810434030628507652))]
1771059330.128 sable_ircd     #x1B[2m2026-02-14T08:55:30.127958Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: GetEvent([EventId(Snowflake(810434030628507652))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [Event { id: EventId(Snowflake(810434030628507652)), timestamp: 1771059330, clock: EventClock(1 => 810434030620119043, 99 => 810434028049412098), target: User(UserId(Snowflake(810434027877044224))), details: UserQuit(UserQuit { message: "Client Quit" }) }]
1771059330.146 1 -> S: PING synchronize358.212621828
1771059330.146 S -> 1: :My.Little.Server 003 jilles :This server was created 2026-02-14 08:55:30.045708568 UTC
1771059330.146 S -> 1: :My.Little.Server 004 jilles My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov
1771059330.147 S -> 1: :My.Little.Server 005 jilles EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server
1771059330.147 S -> 1: :My.Little.Server 422 jilles :MOTD File is missing
1771059330.147 S -> 1: :jilles!r@localhost MODE jilles +
1771059330.147 S -> 1: :My.Little.Server NOTICE jilles :The network is currently running in debug mode. Do not send any sensitive information such as passwords.
1771059330.147 sable_ircd     #x1B[2m2026-02-14T08:55:30.146835Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059330.147 sable_ircd     #x1B[2m2026-02-14T08:55:30.146885Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize358.212621828"
1771059330.147 sable_ircd     #x1B[2m2026-02-14T08:55:30.146979Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server PONG My.Little.Server :synchronize358.212621828
1771059330.147 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize358.212621828
1771059330.147 1 -> S: REGISTER * * sesame
1771059330.148 sable_ircd     #x1B[2m2026-02-14T08:55:30.147547Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059330.148 sable_ircd     #x1B[2m2026-02-14T08:55:30.147588Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"REGISTER * * sesame"
1771059330.148 sable_ircd     #x1B[2m2026-02-14T08:55:30.147794Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Found target peer, sending message #x1B[3mtarget#x1B[0m#x1B[2m=#x1B[0mPeerConfig { name: ServerName("My.Little.Services"), address: "127.0.0.1:54003", fingerprint: "8810c8f1088defe88fa294587a8eac24c133965e" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("jilles"), "sesame")) }
1771059330.148 sable_ircd     #x1B[2m2026-02-14T08:55:30.148027Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1771059329), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("jilles"), "sesame")) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:54003 (127.0.0.1:54003)
1771059330.150 sable_ircd     #x1B[2m2026-02-14T08:55:30.149894Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got send result #x1B[3msend_result#x1B[0m#x1B[2m=#x1B[0mOk(JoinHandle { id: Id(26) })
1771059330.162 sable_services #x1B[2m2026-02-14T08:55:30.162144Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: BulkEvents([Event { id: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: User(UserId(Snowflake(810434027877044224))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434027877044225)), NewUserConnection { user: UserId(Snowflake(810434027877044224)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059329 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: User(UserId(Snowflake(810434027877044224))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434027877044225)), NewUserConnection { user: UserId(Snowflake(810434027877044224)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059329 })) }) }]
1771059330.162 sable_services #x1B[2m2026-02-14T08:55:30.162236Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: BulkEvents([Event { id: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: User(UserId(Snowflake(810434027877044224))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434027877044225)), NewUserConnection { user: UserId(Snowflake(810434027877044224)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059329 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: User(UserId(Snowflake(810434027877044224))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434027877044225)), NewUserConnection { user: UserId(Snowflake(810434027877044224)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059329 })) }) }; event clock=EventClock(1 => 810434027407282177) my clock=EventClock(1 => 810434027407282177, 99 => 810434028049412098)
1771059330.162 sable_services #x1B[2m2026-02-14T08:55:30.162316Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: BulkEvents([Event { id: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: User(UserId(Snowflake(810434027877044224))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434027877044225)), NewUserConnection { user: UserId(Snowflake(810434027877044224)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059329 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(810434030620119043)), timestamp: 1771059330, clock: EventClock(1 => 810434027877044226, 99 => 810434028049412098), target: UserConnection(UserConnectionId(Snowflake(810434027877044225))), details: UserDisconnect(UserDisconnect) }
1771059330.162 sable_services #x1B[2m2026-02-14T08:55:30.162363Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: BulkEvents([Event { id: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: User(UserId(Snowflake(810434027877044224))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434027877044225)), NewUserConnection { user: UserId(Snowflake(810434027877044224)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059329 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(810434030628507652)), timestamp: 1771059330, clock: EventClock(1 => 810434030620119043, 99 => 810434028049412098), target: User(UserId(Snowflake(810434027877044224))), details: UserQuit(UserQuit { message: "Client Quit" }) }
1771059330.162 sable_services #x1B[2m2026-02-14T08:55:30.162407Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: BulkEvents([Event { id: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: User(UserId(Snowflake(810434027877044224))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434027877044225)), NewUserConnection { user: UserId(Snowflake(810434027877044224)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059329 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(810434030645284869)), timestamp: 1771059330, clock: EventClock(1 => 810434030628507652, 99 => 810434028049412098), target: User(UserId(Snowflake(810434030632701954))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434030632701955)), NewUserConnection { user: UserId(Snowflake(810434030632701954)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059330 })) }) }
1771059330.169 sable_services #x1B[2m2026-02-14T08:55:30.168962Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: BulkEvents([Event { id: EventId(Snowflake(810434030628507652)), timestamp: 1771059330, clock: EventClock(1 => 810434030620119043, 99 => 810434028049412098), target: User(UserId(Snowflake(810434027877044224))), details: UserQuit(UserQuit { message: "Client Quit" }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(810434030628507652)), timestamp: 1771059330, clock: EventClock(1 => 810434030620119043, 99 => 810434028049412098), target: User(UserId(Snowflake(810434027877044224))), details: UserQuit(UserQuit { message: "Client Quit" }) }]
1771059330.191 sable_services #x1B[2m2026-02-14T08:55:30.191107Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got remote request #x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mServices(RegisterUser(Nickname("jilles"), "sesame"))
1771059330.191 sable_services #x1B[2m2026-02-14T08:55:30.191142Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got register request #x1B[3maccount_name#x1B[0m#x1B[2m=#x1B[0mNickname("jilles")
1771059330.195 sable_services #x1B[2m2026-02-14T08:55:30.195149Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server::command::user_commands#x1B[0m#x1B[2m:#x1B[0m Successfully created account #x1B[3mnew_account#x1B[0m#x1B[2m=#x1B[0mAccount { id: AccountId(Snowflake(810434031270637568)), name: Nickname("jilles"), authorised_fingerprints: [] }
1771059330.195 sable_services #x1B[2m2026-02-14T08:55:30.195325Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434031287414787)), timestamp: 1771059330, clock: EventClock(1 => 810434030645284869, 99 => 810434028049412098), target: Account(AccountId(Snowflake(810434031270637568))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(810434031270637568)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 810434030645284869, 99 => 810434028049412098) my clock=EventClock(1 => 810434030645284869, 99 => 810434028049412098)
1771059330.196 sable_services #x1B[2m2026-02-14T08:55:30.195641Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434031287414787)), timestamp: 1771059330, clock: EventClock(1 => 810434030645284869, 99 => 810434028049412098), target: Account(AccountId(Snowflake(810434031270637568))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(810434031270637568)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:56379 (127.0.0.1:56379)
1771059330.239 sable_ircd     #x1B[2m2026-02-14T08:55:30.236860Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got targeted message response #x1B[3mresponse#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: TargetedMessageResponse(Services(LogUserIn(AccountId(Snowflake(810434031270637568))))) } }
1771059330.239 sable_ircd     #x1B[2m2026-02-14T08:55:30.237075Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: GetEvent([EventId(Snowflake(810434027877044226))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(810434027877044226))]
1771059330.239 sable_ircd     #x1B[2m2026-02-14T08:55:30.237128Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: GetEvent([EventId(Snowflake(810434027877044226))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [Event { id: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: User(UserId(Snowflake(810434027877044224))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434027877044225)), NewUserConnection { user: UserId(Snowflake(810434027877044224)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059329 })) }) }]
1771059330.239 sable_ircd     #x1B[2m2026-02-14T08:55:30.237594Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): REGISTER SUCCESS jilles :You have successfully registered
1771059330.239 sable_ircd     #x1B[2m2026-02-14T08:55:30.237658Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from async_handlers
1771059330.239 sable_ircd     #x1B[2m2026-02-14T08:55:30.237704Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mStateChange(User(UserId(Snowflake(810434030632701954))), UserLogin(UserLogin { account: Some(AccountId(Snowflake(810434031270637568))) }))
1771059330.239 sable_ircd     #x1B[2m2026-02-14T08:55:30.237857Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434031463174150)), timestamp: 1771059330, clock: EventClock(1 => 810434030645284869, 99 => 810434028049412098), target: User(UserId(Snowflake(810434030632701954))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(810434031270637568))) }) }; event clock=EventClock(1 => 810434030645284869, 99 => 810434028049412098) my clock=EventClock(1 => 810434030645284869, 99 => 810434028049412098)
1771059330.239 sable_ircd     #x1B[2m2026-02-14T08:55:30.238389Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434031463174150)), timestamp: 1771059330, clock: EventClock(1 => 810434030645284869, 99 => 810434028049412098), target: User(UserId(Snowflake(810434030632701954))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(810434031270637568))) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:54003 (127.0.0.1:54003)
1771059330.242 sable_ircd     #x1B[2m2026-02-14T08:55:30.242168Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434031287414787)), timestamp: 1771059330, clock: EventClock(1 => 810434030645284869, 99 => 810434028049412098), target: Account(AccountId(Snowflake(810434031270637568))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(810434031270637568)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434031287414787)), timestamp: 1771059330, clock: EventClock(1 => 810434030645284869, 99 => 810434028049412098), target: Account(AccountId(Snowflake(810434031270637568))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(810434031270637568)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 810434030645284869, 99 => 810434028049412098) my clock=EventClock(1 => 810434031463174150, 99 => 810434028049412098)
1771059330.244 sable_ircd     #x1B[2m2026-02-14T08:55:30.242989Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434031287414787)), timestamp: 1771059330, clock: EventClock(1 => 810434030645284869, 99 => 810434028049412098), target: Account(AccountId(Snowflake(810434031270637568))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(810434031270637568)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434031287414787)), timestamp: 1771059330, clock: EventClock(1 => 810434030645284869, 99 => 810434028049412098), target: Account(AccountId(Snowflake(810434031270637568))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(810434031270637568)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:54003 (127.0.0.1:54003)
1771059330.245 sable_services #x1B[2m2026-02-14T08:55:30.244585Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434031463174150)), timestamp: 1771059330, clock: EventClock(1 => 810434030645284869, 99 => 810434028049412098), target: User(UserId(Snowflake(810434030632701954))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(810434031270637568))) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434031463174150)), timestamp: 1771059330, clock: EventClock(1 => 810434030645284869, 99 => 810434028049412098), target: User(UserId(Snowflake(810434030632701954))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(810434031270637568))) }) }; event clock=EventClock(1 => 810434030645284869, 99 => 810434028049412098) my clock=EventClock(1 => 810434030645284869, 99 => 810434031287414787)
1771059330.245 sable_services #x1B[2m2026-02-14T08:55:30.245200Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434031463174150)), timestamp: 1771059330, clock: EventClock(1 => 810434030645284869, 99 => 810434028049412098), target: User(UserId(Snowflake(810434030632701954))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(810434031270637568))) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434031463174150)), timestamp: 1771059330, clock: EventClock(1 => 810434030645284869, 99 => 810434028049412098), target: User(UserId(Snowflake(810434030632701954))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(810434031270637568))) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:56379 (127.0.0.1:56379)
1771059330.250 sable_ircd     #x1B[2m2026-02-14T08:55:30.249694Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434031463174150)), timestamp: 1771059330, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(810434030632701954)), 3), old_account: None, new_account: Some(AccountId(Snowflake(810434031270637568))) }), users_to_notify: [] })
1771059330.251 sable_ircd     #x1B[2m2026-02-14T08:55:30.251109Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434031463174150)), timestamp: 1771059330, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(810434030632701954)), 3), old_account: None, new_account: Some(AccountId(Snowflake(810434031270637568))) }), users_to_notify: [] }
1771059330.251 sable_ircd     #x1B[2m2026-02-14T08:55:30.251259Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434031463174150)), timestamp: 1771059330, change: EventComplete(EventComplete), users_to_notify: [] })
1771059330.251 sable_ircd     #x1B[2m2026-02-14T08:55:30.251325Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434031463174150)), timestamp: 1771059330, change: EventComplete(EventComplete), users_to_notify: [] }
1771059330.251 sable_ircd     #x1B[2m2026-02-14T08:55:30.251418Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434031287414787)), timestamp: 1771059330, change: EventComplete(EventComplete), users_to_notify: [] })
1771059330.252 sable_ircd     #x1B[2m2026-02-14T08:55:30.251480Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434031287414787)), timestamp: 1771059330, change: EventComplete(EventComplete), users_to_notify: [] }
1771059330.278 sable_services #x1B[2m2026-02-14T08:55:30.278236Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: BulkEvents([Event { id: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: User(UserId(Snowflake(810434027877044224))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434027877044225)), NewUserConnection { user: UserId(Snowflake(810434027877044224)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059329 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(810434027877044226)), timestamp: 1771059329, clock: EventClock(1 => 810434027407282177), target: User(UserId(Snowflake(810434027877044224))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(810434027877044225)), NewUserConnection { user: UserId(Snowflake(810434027877044224)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059329 })) }) }]
1771059330.348 1 -> S: PING synchronize358.41418656
1771059330.348 S -> 1: REGISTER SUCCESS jilles :You have successfully registered
1771059330.348 sable_ircd     #x1B[2m2026-02-14T08:55:30.348351Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059330.348 sable_ircd     #x1B[2m2026-02-14T08:55:30.348416Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize358.41418656"
1771059331.102 sable_ircd     #x1B[2m2026-02-14T08:55:31.102044Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server PONG My.Little.Server :synchronize358.41418656
1771059331.102 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize358.41418656
1771059331.103 1 -> S: QUIT
1771059331.103 sable_ircd     #x1B[2m2026-02-14T08:55:31.102775Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059331.103 sable_ircd     #x1B[2m2026-02-14T08:55:31.102818Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"QUIT"
1771059331.203 1 -> S: PING synchronize359.268858866
1771059331.203 sable_ircd     #x1B[2m2026-02-14T08:55:31.203022Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059331.203 sable_ircd     #x1B[2m2026-02-14T08:55:31.203080Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize359.268858866"
1771059332.203 1: waiting…
1771059332.207 sable_ircd     #x1B[2m2026-02-14T08:55:32.207429Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): ERROR :Client quit
1771059332.208 sable_ircd     #x1B[2m2026-02-14T08:55:32.207565Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mCloseConnection(ConnectionId(ListenerId(0), 3))
1771059332.208 sable_ircd     #x1B[2m2026-02-14T08:55:32.207614Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::connection_collection#x1B[0m#x1B[2m:#x1B[0m Removing connection ConnectionId(ListenerId(0), 3)
1771059332.208 S -> 1: ERROR :Client quit
1771059332.208 sable_ircd     #x1B[2m2026-02-14T08:55:32.207792Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434039725953031)), timestamp: 1771059332, clock: EventClock(1 => 810434031463174150, 99 => 810434031287414787), target: UserConnection(UserConnectionId(Snowflake(810434030632701955))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 810434031463174150, 99 => 810434031287414787) my clock=EventClock(1 => 810434031463174150, 99 => 810434031287414787)
1771059332.208 sable_ircd     #x1B[2m2026-02-14T08:55:32.208152Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434039725953031)), timestamp: 1771059332, clock: EventClock(1 => 810434031463174150, 99 => 810434031287414787), target: UserConnection(UserConnectionId(Snowflake(810434030632701955))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:54003 (127.0.0.1:54003)
1771059332.208 sable_ircd     #x1B[2m2026-02-14T08:55:32.208165Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m Connection error #x1B[3mconnection#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3) #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mClosed
1771059332.208 sable_ircd     #x1B[2m2026-02-14T08:55:32.208262Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059332.211 sable_ircd     #x1B[2m2026-02-14T08:55:32.210453Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434039738535944)), timestamp: 1771059332, clock: EventClock(1 => 810434039725953031, 99 => 810434031287414787), target: User(UserId(Snowflake(810434030632701954))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 810434039725953031, 99 => 810434031287414787) my clock=EventClock(1 => 810434039725953031, 99 => 810434031287414787)
1771059332.211 sable_ircd     #x1B[2m2026-02-14T08:55:32.210722Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434039738535944)), timestamp: 1771059332, clock: EventClock(1 => 810434039725953031, 99 => 810434031287414787), target: User(UserId(Snowflake(810434030632701954))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:54003 (127.0.0.1:54003)
1771059332.211 sable_ircd     #x1B[2m2026-02-14T08:55:32.210839Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434039725953031)), timestamp: 1771059332, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(810434030632701954)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(810434030632701955)), user: UserId(Snowflake(810434030632701954)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059330 } }), users_to_notify: [] })
1771059332.211 sable_ircd     #x1B[2m2026-02-14T08:55:32.210880Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434039725953031)), timestamp: 1771059332, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(810434030632701954)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(810434030632701955)), user: UserId(Snowflake(810434030632701954)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1771059330 } }), users_to_notify: [] }
1771059332.211 sable_ircd     #x1B[2m2026-02-14T08:55:32.210929Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434039725953031)), timestamp: 1771059332, change: EventComplete(EventComplete), users_to_notify: [] })
1771059332.211 sable_ircd     #x1B[2m2026-02-14T08:55:32.210952Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434039725953031)), timestamp: 1771059332, change: EventComplete(EventComplete), users_to_notify: [] }
1771059332.214 sable_ircd     #x1B[2m2026-02-14T08:55:32.214419Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434039738535944)), timestamp: 1771059332, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(810434030632701954)), 3), nickname: Nickname("jilles"), message: "Client Quit", memberships: [] }), users_to_notify: [] })
1771059332.215 sable_ircd     #x1B[2m2026-02-14T08:55:32.214466Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434039738535944)), timestamp: 1771059332, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(810434030632701954)), 3), nickname: Nickname("jilles"), message: "Client Quit", memberships: [] }), users_to_notify: [] }
1771059332.215 sable_ircd     #x1B[2m2026-02-14T08:55:32.214530Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(810434039738535944)), timestamp: 1771059332, change: EventComplete(EventComplete), users_to_notify: [] })
1771059332.215 sable_ircd     #x1B[2m2026-02-14T08:55:32.214569Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(810434039738535944)), timestamp: 1771059332, change: EventComplete(EventComplete), users_to_notify: [] }
1771059332.215 sable_services #x1B[2m2026-02-14T08:55:32.215200Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434039738535944)), timestamp: 1771059332, clock: EventClock(1 => 810434039725953031, 99 => 810434031287414787), target: User(UserId(Snowflake(810434030632701954))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(810434039738535944)), timestamp: 1771059332, clock: EventClock(1 => 810434039725953031, 99 => 810434031287414787), target: User(UserId(Snowflake(810434030632701954))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 810434039725953031, 99 => 810434031287414787) my clock=EventClock(1 => 810434031463174150, 99 => 810434031287414787)
1771059332.215 sable_services #x1B[2m2026-02-14T08:55:32.215258Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434039738535944)), timestamp: 1771059332, clock: EventClock(1 => 810434039725953031, 99 => 810434031287414787), target: User(UserId(Snowflake(810434030632701954))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(810434039725953031))]
1771059332.216 sable_services #x1B[2m2026-02-14T08:55:32.215587Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434039738535944)), timestamp: 1771059332, clock: EventClock(1 => 810434039725953031, 99 => 810434031287414787), target: User(UserId(Snowflake(810434030632701954))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434039738535944)), timestamp: 1771059332, clock: EventClock(1 => 810434039725953031, 99 => 810434031287414787), target: User(UserId(Snowflake(810434030632701954))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:56379 (127.0.0.1:56379)
1771059332.251 sable_services #x1B[2m2026-02-14T08:55:32.250985Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434039725953031)), timestamp: 1771059332, clock: EventClock(1 => 810434031463174150, 99 => 810434031287414787), target: UserConnection(UserConnectionId(Snowflake(810434030632701955))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(810434039725953031)), timestamp: 1771059332, clock: EventClock(1 => 810434031463174150, 99 => 810434031287414787), target: UserConnection(UserConnectionId(Snowflake(810434030632701955))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 810434031463174150, 99 => 810434031287414787) my clock=EventClock(1 => 810434031463174150, 99 => 810434031287414787)
1771059332.251 sable_services #x1B[2m2026-02-14T08:55:32.251061Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434039725953031)), timestamp: 1771059332, clock: EventClock(1 => 810434031463174150, 99 => 810434031287414787), target: UserConnection(UserConnectionId(Snowflake(810434030632701955))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(810434039738535944)), timestamp: 1771059332, clock: EventClock(1 => 810434039725953031, 99 => 810434031287414787), target: User(UserId(Snowflake(810434030632701954))), details: UserQuit(UserQuit { message: "Client Quit" }) }
1771059332.251 sable_services #x1B[2m2026-02-14T08:55:32.251376Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434039725953031)), timestamp: 1771059332, clock: EventClock(1 => 810434031463174150, 99 => 810434031287414787), target: UserConnection(UserConnectionId(Snowflake(810434030632701955))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1771059329), content: NewEvent(Event { id: EventId(Snowflake(810434039725953031)), timestamp: 1771059332, clock: EventClock(1 => 810434031463174150, 99 => 810434031287414787), target: UserConnection(UserConnectionId(Snowflake(810434030632701955))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:56379 (127.0.0.1:56379)
1771059332.257 sable_ircd     #x1B[2m2026-02-14T08:55:32.256976Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: GetEvent([EventId(Snowflake(810434039725953031))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(810434039725953031))]
1771059332.257 sable_ircd     #x1B[2m2026-02-14T08:55:32.257029Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1771059329), content: GetEvent([EventId(Snowflake(810434039725953031))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [Event { id: EventId(Snowflake(810434039725953031)), timestamp: 1771059332, clock: EventClock(1 => 810434031463174150, 99 => 810434031287414787), target: UserConnection(UserConnectionId(Snowflake(810434030632701955))), details: UserDisconnect(UserDisconnect) }]
1771059332.298 sable_services #x1B[2m2026-02-14T08:55:32.297962Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1771059329), content: BulkEvents([Event { id: EventId(Snowflake(810434039725953031)), timestamp: 1771059332, clock: EventClock(1 => 810434031463174150, 99 => 810434031287414787), target: UserConnection(UserConnectionId(Snowflake(810434030632701955))), details: UserDisconnect(UserDisconnect) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(810434039725953031)), timestamp: 1771059332, clock: EventClock(1 => 810434031463174150, 99 => 810434031287414787), target: UserConnection(UserConnectionId(Snowflake(810434030632701955))), details: UserDisconnect(UserDisconnect) }]
1771059332.308 1 -> S: PING synchronize360.374338403
1771059332.309 1: connects to server.
1771059332.309 1 -> S: CAP LS 302
1771059332.309 sable_ircd     #x1B[2m2026-02-14T08:55:32.308830Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m got new connection #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0mConnectionData { id: ConnectionId(ListenerId(0), 4), remote_addr: 127.0.0.1, tls_info: None }
1771059332.309 sable_ircd     #x1B[2m2026-02-14T08:55:32.308951Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059332.309 sable_ircd     #x1B[2m2026-02-14T08:55:32.308990Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection
1771059332.309 sable_ircd     #x1B[2m2026-02-14T08:55:32.309036Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server NOTICE * :*** Looking up your hostname
1771059332.309 sable_ircd     #x1B[2m2026-02-14T08:55:32.309183Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059332.309 sable_ircd     #x1B[2m2026-02-14T08:55:32.309241Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"CAP LS 302"
1771059332.309 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname
1771059332.309 sable_ircd     #x1B[2m2026-02-14T08:55:32.309360Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server CAP * LS :message-tags server-time echo-message sasl=PLAIN,EXTERNAL batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename
1771059332.310 S -> 1: :My.Little.Server CAP * LS :message-tags server-time echo-message sasl=PLAIN,EXTERNAL batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename
1771059332.310 1 -> S: CAP REQ :extended-monitor account-notify
1771059332.310 sable_ircd     #x1B[2m2026-02-14T08:55:32.310050Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events
1771059332.310 sable_ircd     #x1B[2m2026-02-14T08:55:32.310087Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"CAP REQ :extended-monitor account-notify"
1771059332.310 sable_ircd     #x1B[2m2026-02-14T08:55:32.310161Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server CAP * NAK :extended-monitor account-notify
1771059332.310 sable_ircd     #x1B[2m2026-02-14T08:55:32.310207Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from auth_events
1771059332.310 sable_ircd     #x1B[2m2026-02-14T08:55:32.310227Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m DNS lookup finished for ConnectionId(ListenerId(0), 4): 127.0.0.1/Some(Hostname("localhost"))
1771059332.310 sable_ircd     #x1B[2m2026-02-14T08:55:32.310247Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server NOTICE * :*** Found your hostname: localhost
1771059332.310 sable_ircd     #x1B[2m2026-02-14T08:55:32.310265Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 360, tv_nsec: 375275817 }, attach_user_id: OnceLock(<uninit>), user: OnceLock(<uninit>), extra_user_params: OnceLock(<uninit>), nick: OnceLock(<uninit>), realname: OnceLock(<uninit>), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(<uninit>), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse
1771059332.311 S -> 1: :My.Little.Server CAP * NAK :extended-monitor account-notify
1771059332.313 sable_ircd     #x1B[2m2026-02-14T08:55:32.312949Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error in outbound network sync connection: I/O error: unexpected end of file
1771059332.313 sable_ircd     #x1B[2m2026-02-14T08:55:32.313121Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1mhandle_connection#x1B[0m#x1B[1m{#x1B[0m#x1B[3mconn#x1B[0m#x1B[2m=#x1B[0mPollEvented { io: Some(TcpStream { addr: 127.0.0.1:56379, peer: 127.0.0.1:53501, fd: 19 }) } #x1B[3mmessage_sender#x1B[0m#x1B[2m=#x1B[0mUnboundedSender { chan: Tx { inner: Chan { tx: Tx { block_tail: 0x55e623854010, tail_position: 0 }, semaphore: Semaphore(0), rx_waker: AtomicWaker, tx_count: 2, rx_fields: "..." } } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error handling message: I/O error: unexpected end of file
1771059332.318 1: disconnects from server.